**** dT 0.000 * top TEST ../../../../bin/vinyltest/tests/r02702.vtc starting **** top extmacro def pkg_version=trunk **** top extmacro def pkg_branch=trunk **** top extmacro def pwd=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest **** top extmacro def date(...) **** top extmacro def string(...) **** top extmacro def localhost=127.0.0.1 **** top extmacro def bad_backend=127.0.0.1:34246 **** top extmacro def listen_addr=127.0.0.1:0 **** top extmacro def bad_ip=192.0.2.255 **** top extmacro def topbuild=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub **** top extmacro def topsrc=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/../.. **** top macro def testdir=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/../../../../bin/vinyltest/tests **** top macro def tmpdir=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa **** top macro def vtcid=vtc.743877.3a22fdaa ** top === vtest "probes to UDS backends with .proxy_header in [12]" * top VTEST probes to UDS backends with .proxy_header in [12] ** top === server s1 -listen "${tmpdir}/s1.sock" { ** s1 Starting server **** dT 0.001 **** s1 macro def s1_addr=0.0.0.0 **** s1 macro def s1_port=0 **** s1 macro def s1_sock=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/s1.sock * s1 Listen on /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/s1.sock ** top === vinyl v1 -vcl { ** s1 Started on /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/s1.sock (1 iterations) **** dT 0.013 ** v1 Launch *** v1 CMD: cd ${pwd} && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 56674' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v1/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: *** v1 CMD: cd /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 56674' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v1/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: **** dT 0.014 *** v1 PID: 743904 **** v1 macro def v1_pid=743904 **** v1 macro def v1_name=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v1 **** dT 0.052 *** v1 debug|Warning: mlock() of VSM failed: Not owner (1 *** v1 debug|) **** dT 0.055 *** v1 debug|Debug: Version: vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v1 debug| *** v1 debug|Debug: *** v1 debug|Platform: -jsolaris,-sdefault,-sdefault,-hcritbit *** v1 debug|200 292 *** v1 debug|----------------------------- *** v1 debug|Vinyl Cache CLI 1.0 *** v1 debug|----------------------------- *** v1 debug|-jsolaris,-sdefault,-sdefault,-hcritbit *** v1 debug|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v1 debug| *** v1 debug|Type 'help' for command list. *** v1 debug|Type 'quit' to close CLI session. *** v1 debug|Type 'start' to launch worker process. *** v1 debug| **** dT 0.152 **** v1 CLIPOLL 1 0x1 0x0 0x0 *** v1 CLI connection fd = 6 **** dT 0.153 *** v1 CLI RX 107 **** v1 CLI RX|awkhaosdopjqpdhchuyazlkneerhdbnl **** v1 CLI RX| **** v1 CLI RX|Authentication required. **** v1 CLI TX|auth 7f73a93aacf00aa746b6a2e90def0377603a3acf744a44f1dded5096b06c4a71 **** dT 0.154 *** v1 CLI RX 200 **** v1 CLI RX|----------------------------- **** v1 CLI RX|Vinyl Cache CLI 1.0 **** v1 CLI RX|----------------------------- **** v1 CLI RX|-jsolaris,-sdefault,-sdefault,-hcritbit **** v1 CLI RX|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 **** v1 CLI RX| **** v1 CLI RX|Type 'help' for command list. **** v1 CLI RX|Type 'quit' to close CLI session. **** v1 CLI RX|Type 'start' to launch worker process. **** v1 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P **** v1 CLI TX|vcl 4.1; **** v1 CLI TX| **** v1 CLI TX|\tbackend s1 { **** v1 CLI TX|\t\t.path = "/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/s1.sock"; **** v1 CLI TX|\t\t.proxy_header = 1; **** v1 CLI TX| **** v1 CLI TX|\t\t.probe = { **** v1 CLI TX|\t\t\t.window = 1; **** v1 CLI TX|\t\t\t.threshold = 1; **** v1 CLI TX|\t\t\t.interval = 0.5s; **** v1 CLI TX|\t\t} **** v1 CLI TX|\t} **** v1 CLI TX| **** v1 CLI TX|%XJEIFLH|)Xspa8P **** dT 0.255 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.355 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.455 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.555 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.655 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.755 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.855 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.936 *** v1 CLI RX 200 **** v1 CLI RX|Message from VCC-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from C-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from dlopen: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|VCL compiled. **** v1 CLI TX|vcl.use vcl1 *** v1 CLI RX 200 **** v1 CLI RX|VCL 'vcl1' now active ** v1 Start **** v1 CLI TX|start **** dT 0.948 *** v1 debug|Debug: *** v1 debug| Child (744252) Started **** dT 0.980 *** v1 debug|Child launched OK **** dT 0.982 *** s1 accepted fd 4 0.0.0.0 0 ** s1 === rxreq *** v1 CLI RX 200 *** v1 wait-running **** v1 CLI TX|status *** v1 debug|Info: Child (744252) said Child starts *** v1 debug| *** v1 debug|Info: *** v1 debug| *** v1 debug|Child (744252) said Security: proc_setid missing, uid/gid unchanged *** v1 debug| *** v1 CLI RX 200 **** v1 CLI RX|Child in state running **** v1 CLI TX|debug.listen_address *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 59618 **** v1 CLI TX|debug.xid 1000 **** s1 rxhdr|PROXY UNKNOWN\r **** s1 rxhdr|GET / HTTP/1.1\r **** s1 rxhdr|Host: 0.0.0.0\r **** s1 rxhdr|Connection: close\r **** s1 rxhdr|\r **** s1 rxhdrlen = 67 **** s1 http[ 0] |PROXY **** s1 http[ 1] |UNKNOWN **** s1 http[ 2] (null) **** s1 http[ 3] |GET / HTTP/1.1 **** s1 http[ 4] |Host: 0.0.0.0 *** v1 CLI RX 200 **** s1 http[ 5] |Connection: close **** v1 CLI RX|XID is 1000 chunk 1 **** v1 CLI TX|debug.listen_address **** s1 bodylen = 0 ** s1 === txresp **** s1 txresp|HTTP/1.1 200 OK\r **** s1 txresp|Date: Tue, 17 Mar 2026 12:21:24 GMT\r **** s1 txresp|Server: s1\r **** s1 txresp|Content-Length: 0\r **** s1 txresp|\r *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 59618 ** v1 Listen on 127.0.0.1 59618 *** s1 shutting fd 4 (server run) **** v1 macro def v1_addr=127.0.0.1 **** v1 macro def v1_port=59618 **** v1 macro def v1_sock=127.0.0.1:59618 **** v1 macro def v1_a0_addr=127.0.0.1 **** v1 macro def v1_a0_port=59618 **** v1 macro def v1_a0_sock=127.0.0.1:59618 ** s1 Ending **** dT 1.055 **** v1 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1773750083.722163/vgc.so 1auto **** v1 vsl| 0 Backend_health - s1 Went sick -------- 0 1 1 0.000000 0.000000 "" **** v1 vsl| 0 Backend_health - s1 Still sick -------- 0 1 1 0.000000 0.000000 "" **** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1773750083.722163/vgc.so" as "vcl1" **** v1 vsl| 0 CLI - Rd vcl.use "vcl1" **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd start **** v1 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:59618 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:59618 **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 59618 **** v1 vsl| 0 CLI - Rd debug.xid 1000 **** v1 vsl| 0 CLI - Wr 200 19 XID is 1000 chunk 1 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 59618 **** v1 vsl| 0 Backend_health - s1 Went healthy --U-X-RH 1 1 1 0.000750 0.000750 "HTTP/1.1 200 OK" **** dT 1.082 ** top === delay 1 *** top delaying 1 second(s) **** dT 2.083 ** top === vinyl v1 -cliexpect "vcl1.s1[ ]+probe[ ]+1/1[ ]+healthy" bac... **** v1 CLI TX|backend.list **** dT 2.084 *** v1 CLI RX 200 **** v1 CLI RX|Backend name Admin Probe Health Last change **** v1 CLI RX|vcl1.s1 probe 1/1 healthy Tue, 17 Mar 2026 12:21:24 GMT ** v1 CLI 200 ** top === server s2 { ** s2 Starting server **** s2 macro def s2_addr=127.0.0.1 **** s2 macro def s2_port=46883 **** s2 macro def s2_sock=127.0.0.1:46883 * s2 Listen on 127.0.0.1:46883 ** top === vinyl v2 -arg "-a ${tmpdir}/v2.sock,PROXY,mode=0777" -vcl { **** dT 2.085 ** s2 Started on 127.0.0.1:46883 (1 iterations) **** dT 2.095 ** v2 Launch *** v2 CMD: cd ${pwd} && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2 -i v2 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -M '127.0.0.1 54931' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: -a /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock,PROXY,mode=0777 *** v2 CMD: cd /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld -d -n /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2 -i v2 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -M '127.0.0.1 54931' -P /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2/vinyld.pid -p vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: -a /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock,PROXY,mode=0777 *** v2 PID: 744882 **** v2 macro def v2_pid=744882 **** v2 macro def v2_name=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2 **** dT 2.132 *** v2 debug|Warning: mlock() of VSM failed: Not owner (1) **** dT 2.135 *** v2 debug|Debug: Version: vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v2 debug| *** v2 debug|Debug: *** v2 debug|Platform: -jsolaris,-sdefault,-sdefault,-hcritbit *** v2 debug|200 292 *** v2 debug|----------------------------- *** v2 debug|Vinyl Cache CLI 1.0 *** v2 debug|----------------------------- *** v2 debug|-jsolaris,-sdefault,-sdefault,-hcritbit *** v2 debug|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v2 debug| *** v2 debug|Type 'help' for command list. *** v2 debug|Type 'quit' to close CLI session. *** v2 debug|Type 'start' to launch worker process. *** v2 debug| **** dT 2.157 **** v1 vsl| 0 CLI - Rd backend.list **** v1 vsl| 0 CLI - Wr 200 124 Backend name Admin Probe Health Last change vcl1.s1 probe 1/1 healthy Tue, 17 Mar 2026 12:21:24 GMT **** dT 2.232 **** v2 CLIPOLL 1 0x1 0x0 0x0 *** v2 CLI connection fd = 18 **** dT 2.233 *** v2 CLI RX 107 **** v2 CLI RX|mzmysdadjgwmvyffutpixixiswnqpxsf **** v2 CLI RX| **** v2 CLI RX|Authentication required. **** dT 2.234 **** v2 CLI TX|auth ac34541b2aaf262cbf8fc9e82bbaf90540d9ca4dbd3a9733ebec16190bd8ac26 *** v2 CLI RX 200 **** v2 CLI RX|----------------------------- **** v2 CLI RX|Vinyl Cache CLI 1.0 **** v2 CLI RX|----------------------------- **** v2 CLI RX|-jsolaris,-sdefault,-sdefault,-hcritbit **** v2 CLI RX|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 **** v2 CLI RX| **** v2 CLI RX|Type 'help' for command list. **** v2 CLI RX|Type 'quit' to close CLI session. **** v2 CLI RX|Type 'start' to launch worker process. **** dT 2.235 **** v2 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P **** v2 CLI TX|vcl 4.1; **** v2 CLI TX| **** v2 CLI TX|\tbackend s2 { .host = "127.0.0.1"; .port = "46883"; } **** v2 CLI TX| **** v2 CLI TX|%XJEIFLH|)Xspa8P **** dT 2.335 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 2.435 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 2.535 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 2.635 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 2.735 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 2.835 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 2.936 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 3.036 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 3.130 *** v2 CLI RX 200 **** v2 CLI RX|Message from VCC-compiler: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|Message from C-compiler: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|Message from dlopen: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|VCL compiled. **** v2 CLI TX|vcl.use vcl1 *** v2 CLI RX 200 **** v2 CLI RX|VCL 'vcl1' now active ** v2 Start **** v2 CLI TX|start **** dT 3.136 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 3.146 *** v2 debug|Debug: *** v2 debug| Child (745384) Started **** dT 3.181 *** v2 debug|Child launched OK **** dT 3.185 *** v2 debug|Error: *** v2 debug|Child (745384) not responding to CLI, killed it. *** v2 debug|Error: *** v2 debug|Child (745384) Acceptor start failed: *** v2 debug|CLI communication error (hdr) *** v2 debug|Debug: *** v2 debug|Stopping Child *** v2 debug| *** v2 debug|Info: Child (745384) said Child starts *** v2 debug| *** v2 debug|Info: *** v2 debug| *** v2 debug|Child (745384) said Security: proc_setid missing, uid/gid unchanged *** v2 debug| **** dT 3.236 **** v2 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1773750085.802509/vgc.so 1auto **** v2 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1773750085.802509/vgc.so" as "vcl1" **** v2 vsl| 0 CLI - Rd vcl.use "vcl1" **** v2 vsl| 0 CLI - Wr 200 0 **** v2 vsl| 0 CLI - Rd start **** v2 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock **** v2 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock **** v2 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock **** v2 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock **** dT 3.285 *** v2 debug|Error: Child (745384) died signal=6 *** v2 debug| *** v2 debug|Error: *** v2 debug|Child (745384) Panic at: Tue, 17 Mar 2026 12:21:26 GMT *** v2 debug|Wrong turn at ../../../../bin/vinyld/acceptor/cache_acceptor.c:192: *** v2 debug|pthread_create(&VCA_thread, ((void *)0), vca_acct, ((void *)0)) failed *** v2 debug|version = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0 *** v2 debug|ident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports *** v2 debug|now = 5962163.873897 (mono), 1773750086.749954 (real) *** v2 debug|Backtrace: *** v2 debug| 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3] *** v2 debug| 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4] *** v2 debug| 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd] *** v2 debug| 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020] *** v2 debug| 81495b9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/ *** v2 debug|bin/vinyld/vinyld'VAS_Fail+0x3a [0x81495b9] *** v2 debug| 8072e9f: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCA_Start+0x104 [0x8072e9f] *** v2 debug| 80a8879: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'ccf_child_start+0x11 [0x80a8879] *** v2 debug| 814b159: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_dispatch+0x2ec [0x814b159] *** v2 debug| 814b3cb: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_exec+0x260 [0x814b3cb] *** v2 debug| 814b8a8: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_feed+0x392 [0x814b8a8] *** v2 debug| 814c846: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCLS_Poll+0x2a4 [0x814c846] *** v2 debug| 808682f: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'CLI_Run+0xae [0x808682f] *** v2 debug| 80a9030: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-c *** v2 debug|ache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'child_main+0x3cb [0x80a9030] *** v2 debug| 80f805e: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'mgt_launch_child+0x3f8 [0x80f805e] *** v2 debug| 80f8e52: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'mch_cli_server_start+0x28 [0x80f8e52] *** v2 debug| 814b159: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_dispatch+0x2ec [0x814b159] *** v2 debug| 814b3cb: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_exec+0x260 [0x814b3cb] *** v2 debug| 814b8a8: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_feed+0x392 [0x814b8a8] *** v2 debug| 814c846: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCLS_Poll+0x2a4 [0x814c846] *** v2 debug| 80f9b14: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'mgt_cli_callback2+0x1d [0x80 *** v2 debug|f9b14] *** v2 debug|errno = 11 (Resource temporarily unavailable) *** v2 debug|argv = { *** v2 debug| [0] = \"vinyld\", *** v2 debug| [1] = \"-d\", *** v2 debug| [2] = \"-n\", *** v2 debug| [3] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2\", *** v2 debug| [4] = \"-i\", *** v2 debug| [5] = \"v2\", *** v2 debug| [6] = \"-l\", *** v2 debug| [7] = \"2m\", *** v2 debug| [8] = \"-p\", *** v2 debug| [9] = \"auto_restart=off\", *** v2 debug| [10] = \"-p\", *** v2 debug| [11] = \"syslog_cli_traffic=off\", *** v2 debug| [12] = \"-p\", *** v2 debug| [13] = \"thread_pool_min=10\", *** v2 debug| [14] = \"-p\", *** v2 debug| [15] = \"debug=+vtc_mode\", *** v2 debug| [16] = \"-p\", *** v2 debug| [17] = \"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\", *** v2 debug| [18] = \"-p\", *** v2 debug| [19] = \"h2_initial_window_size=1m\", *** v2 debug| [20] = \"-p\", *** v2 debug| [21] = \"h2_rx_window_low_water=64k\", *** v2 debug| [22] = \"-M\", *** v2 debug| [23] = \"127.0.0.1 54931\", *** v2 debug| [24] = \"-P\", *** v2 debug| [25] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2/vinyld.pid\", *** v2 debug| [26] = \"-p\", *** v2 debug| [27] = \"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\", *** v2 debug| [28] = \"-a\", *** v2 debug| [29] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock,PROXY, *** v2 debug|mode=0777\", *** v2 debug|} *** v2 debug|pthread.self = 1 *** v2 debug|pthread.name = (cache-main) *** v2 debug|thr.req = NULL *** v2 debug|thr.busyobj = NULL *** v2 debug|thr.worker = NULL *** v2 debug|vmods = { *** v2 debug|}, *** v2 debug|pools = { *** v2 debug| pool = 827f078 { *** v2 debug| nidle = 9, *** v2 debug| nthr = 10, *** v2 debug| lqueue = 0 *** v2 debug| }, *** v2 debug| pool = 82bf9e0 { *** v2 debug| nidle = 9, *** v2 debug| nthr = 10, *** v2 debug| lqueue = 0 *** v2 debug| }, *** v2 debug|}, *** v2 debug| *** v2 debug| *** v2 debug|Debug: Child cleanup complete *** v2 CLI RX 400 **** v2 CLI RX|Child (745384) Acceptor start failed: **** v2 CLI RX|CLI communication error (hdr) **** dT 3.295 ---- v2 CLI start command failed: 400 Child (745384) Acceptor start failed: CLI communication error (hdr) * top RESETTING after ../../../../bin/vinyltest/tests/r02702.vtc ** s1 Waiting for server (3/-1) ** s2 Waiting for server (4/-1) **** dT 3.296 ** v1 Wait **** v1 CLI TX|panic.show *** v1 CLI RX 300 **** v1 CLI RX|Child has not panicked or panic has been cleared *** v1 debug|Info: manager stopping child *** v1 debug|Debug: Stopping Child **** dT 3.357 **** v1 vsl| 0 Backend_health - s1 Went sick --U-Xr-- 0 1 1 0.000000 0.000750 "Read error 146 (Connection refused)" **** v1 vsl| 0 CLI - EOF on CLI connection, worker stops **** dT 3.396 *** v1 debug|Info: Child (744252) said Child dies *** v1 debug|Info: Child (744252) ended *** v1 debug|Debug: *** v1 debug|Child cleanup complete *** v1 debug|Info: *** v1 debug|manager dies **** v1 STDOUT EOF **** dT 3.458 ** v1 WAIT4 pid=743904 status=0x0000 (user 0.691000 sys 0.144000) ** v2 Wait **** v2 CLI TX|panic.show *** v2 CLI RX 200 **** v2 CLI RX|Child (745384) Panic at: Tue, 17 Mar 2026 12:21:26 GMT **** v2 CLI RX|Wrong turn at ../../../../bin/vinyld/acceptor/cache_acceptor.c:192: **** v2 CLI RX|pthread_create(&VCA_thread, ((void *)0), vca_acct, ((void *)0)) failed **** v2 CLI RX|version = vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4, vrt api = 23.0 **** v2 CLI RX|ident = -jsolaris,-sdefault,-sdefault,-hcritbit,ports **** v2 CLI RX|now = 5962163.873897 (mono), 1773750086.749954 (real) **** v2 CLI RX|Backtrace: **** v2 CLI RX| 8149fb3: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'vbt_execinfo+0x39 [0x8149fb3] **** v2 CLI RX| 814a1c4: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VBT_format+0x2d [0x814a1c4] **** v2 CLI RX| 80aecdd: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_backtrace+0x34 [0x80aecdd] **** v2 CLI RX| 80af020: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'pan_ic+0x27c [0x80af020] **** v2 CLI RX| 81495b9: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VAS_Fail+0x3a [0x81495b9] **** v2 CLI RX| 8072e9f: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCA_Start+0x104 [0x8072e9f] **** v2 CLI RX| 80a8879: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'ccf_child_start+0x11 [0x80a8879] **** v2 CLI RX| 814b159: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_dispatch+0x2ec [0x814b159] **** v2 CLI RX| 814b3cb: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_exec+0x260 [0x814b3cb] **** v2 CLI RX| 814b8a8: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_feed+0x392 [0x814b8a8] **** v2 CLI RX| 814c846: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCLS_Poll+0x2a4 [0x814c846] **** v2 CLI RX| 808682f: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'CLI_Run+0xae [0x808682f] **** v2 CLI RX| 80a9030: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'child_main+0x3cb [0x80a9030] **** v2 CLI RX| 80f805e: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'mgt_launch_child+0x3f8 [0x80f805e] **** v2 CLI RX| 80f8e52: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'mch_cli_server_start+0x28 [0x80f8e52] **** v2 CLI RX| 814b159: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_dispatch+0x2ec [0x814b159] **** v2 CLI RX| 814b3cb: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_exec+0x260 [0x814b3cb] **** v2 CLI RX| 814b8a8: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'cls_feed+0x392 [0x814b8a8] **** v2 CLI RX| 814c846: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'VCLS_Poll+0x2a4 [0x814c846] **** v2 CLI RX| 80f9b14: /tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyld/vinyld'mgt_cli_callback2+0x1d [0x80f9b14] **** v2 CLI RX|errno = 11 (Resource temporarily unavailable) **** v2 CLI RX|argv = { **** v2 CLI RX| [0] = \"vinyld\", **** v2 CLI RX| [1] = \"-d\", **** v2 CLI RX| [2] = \"-n\", **** v2 CLI RX| [3] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2\", **** v2 CLI RX| [4] = \"-i\", **** v2 CLI RX| [5] = \"v2\", **** v2 CLI RX| [6] = \"-l\", **** v2 CLI RX| [7] = \"2m\", **** v2 CLI RX| [8] = \"-p\", **** v2 CLI RX| [9] = \"auto_restart=off\", **** v2 CLI RX| [10] = \"-p\", **** v2 CLI RX| [11] = \"syslog_cli_traffic=off\", **** v2 CLI RX| [12] = \"-p\", **** v2 CLI RX| [13] = \"thread_pool_min=10\", **** v2 CLI RX| [14] = \"-p\", **** v2 CLI RX| [15] = \"debug=+vtc_mode\", **** v2 CLI RX| [16] = \"-p\", **** v2 CLI RX| [17] = \"vsl_mask=+Debug,+H2RxHdr,+H2RxBody\", **** v2 CLI RX| [18] = \"-p\", **** v2 CLI RX| [19] = \"h2_initial_window_size=1m\", **** v2 CLI RX| [20] = \"-p\", **** v2 CLI RX| [21] = \"h2_rx_window_low_water=64k\", **** v2 CLI RX| [22] = \"-M\", **** v2 CLI RX| [23] = \"127.0.0.1 54931\", **** v2 CLI RX| [24] = \"-P\", **** v2 CLI RX| [25] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2/vinyld.pid\", **** v2 CLI RX| [26] = \"-p\", **** v2 CLI RX| [27] = \"vmod_path=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs:\", **** v2 CLI RX| [28] = \"-a\", **** v2 CLI RX| [29] = \"/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.743877.3a22fdaa/v2.sock,PROXY,mode=0777\", **** v2 CLI RX|} **** v2 CLI RX|pthread.self = 1 **** v2 CLI RX|pthread.name = (cache-main) **** v2 CLI RX|thr.req = NULL **** v2 CLI RX|thr.busyobj = NULL **** v2 CLI RX|thr.worker = NULL **** v2 CLI RX|vmods = { **** v2 CLI RX|}, **** v2 CLI RX|pools = { **** v2 CLI RX| pool = 827f078 { **** v2 CLI RX| nidle = 9, **** v2 CLI RX| nthr = 10, **** v2 CLI RX| lqueue = 0 **** v2 CLI RX| }, **** v2 CLI RX| pool = 82bf9e0 { **** v2 CLI RX| nidle = 9, **** v2 CLI RX| nthr = 10, **** v2 CLI RX| lqueue = 0 **** v2 CLI RX| }, **** v2 CLI RX|}, **** v2 CLI RX| **** v2 CLI RX| **** dT 3.468 ---- v2 Unexpected panic * top failure during reset # top TEST ../../../../bin/vinyltest/tests/r02702.vtc FAILED (3.471) exit=2 FAIL tests/r02702.vtc (exit status: 2)